bng-test/usr/local/etc/raddb# cat users
# 000c.29eb.eb96        Cleartext-Password := "123"
# 000c.297c.ea3f        Cleartext-Password := "123"

user1                   Cleartext-Password := "pass1"

spirent0                Cleartext-Password := "spirent0"

spirent1                Cleartext-Password := "spirent1"

===

rad_recv: Access-Request packet from host 192.168.3.74 port 53233, id=113, length=246
        User-Name = "spirent0"
        Service-Type = Framed-User
        Framed-Protocol = PPP
        CHAP-Password = 0xb90fe01775e97ac45f3d014fd5488c2a24
        CHAP-Challenge = 0xcca49a4dba519e6a8f24fb3ff9546f673bd9185fd23a7d1d
        Chargeable-User-Identity = ""
        Acct-Session-Id = "34"
        Calling-Station-Id = "MX104-RE0:ps0.1073741837-0/0/0.0:11"
        ERX-Dhcp-Mac-Addr = "0010.9400.0007"
        ERX-Interface-Desc = "-- (P)seudowire (S)ervice interface"
        NAS-Identifier = "MX104-RE0"
        NAS-Port = 11
        NAS-Port-Id = "ps0.1073741837-0/0/0.0:11"
        NAS-Port-Type = Ethernet
# Executing section authorize from file /usr/local/etc/raddb/sites-enabled/default
+group authorize {
++[preprocess] = ok
[chap] Setting 'Auth-Type := CHAP'
++[chap] = ok
++[mschap] = noop
++[digest] = noop
[suffix] No '@' in User-Name = "spirent0", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] = noop
[eap] No EAP-Message, not doing EAP
++[eap] = noop
[files] users: Matched entry spirent0 at line 6
++[files] = ok
++[expiration] = noop
++[logintime] = noop
[pap] WARNING: Auth-Type already set.  Not setting to PAP
++[pap] = noop
+} # group authorize = ok
Found Auth-Type = CHAP
# Executing group from file /usr/local/etc/raddb/sites-enabled/default
+group CHAP {
[chap] login attempt by "spirent0" with CHAP password
[chap] Using clear text password "spirent0" for user spirent0 authentication.
[chap] chap user spirent0 authenticated succesfully
++[chap] = ok
+} # group CHAP = ok
Login OK: [spirent0/<CHAP-Password>] (from client mx104-RE0 port 11 cli MX104-RE0:ps0.1073741837-0/0/0.0:11)
# Executing section post-auth from file /usr/local/etc/raddb/sites-enabled/default
+group post-auth {
++[exec] = noop
+} # group post-auth = noop
Sending Access-Accept of id 113 to 192.168.3.74 port 53233
Finished request 0.
Going to the next request
Waking up in 4.9 seconds.
rad_recv: Access-Request packet from host 192.168.3.74 port 53233, id=114, length=251
        User-Name = "spirent1"
        Service-Type = Framed-User
        Framed-Protocol = PPP
        CHAP-Password = 0x9575a929d71e084ae30da89d0953260019
        CHAP-Challenge = 0xf075a26a3099207140c188426f67c5554fb32c0d82f2c120080914276f
        Chargeable-User-Identity = ""
        Acct-Session-Id = "35"
        Calling-Station-Id = "MX104-RE0:ps0.1073741837-0/0/0.0:11"
        ERX-Dhcp-Mac-Addr = "0010.9400.0008"
        ERX-Interface-Desc = "-- (P)seudowire (S)ervice interface"
        NAS-Identifier = "MX104-RE0"
        NAS-Port = 11
        NAS-Port-Id = "ps0.1073741837-0/0/0.0:11"
        NAS-Port-Type = Ethernet
# Executing section authorize from file /usr/local/etc/raddb/sites-enabled/default
+group authorize {
++[preprocess] = ok
[chap] Setting 'Auth-Type := CHAP'
++[chap] = ok
++[mschap] = noop
++[digest] = noop
[suffix] No '@' in User-Name = "spirent1", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] = noop
[eap] No EAP-Message, not doing EAP
++[eap] = noop
[files] users: Matched entry spirent1 at line 8
++[files] = ok
++[expiration] = noop
++[logintime] = noop
[pap] WARNING: Auth-Type already set.  Not setting to PAP
++[pap] = noop
+} # group authorize = ok
Found Auth-Type = CHAP
# Executing group from file /usr/local/etc/raddb/sites-enabled/default
+group CHAP {
[chap] login attempt by "spirent1" with CHAP password
[chap] Using clear text password "spirent1" for user spirent1 authentication.
[chap] chap user spirent1 authenticated succesfully
++[chap] = ok
+} # group CHAP = ok
Login OK: [spirent1/<CHAP-Password>] (from client mx104-RE0 port 11 cli MX104-RE0:ps0.1073741837-0/0/0.0:11)
# Executing section post-auth from file /usr/local/etc/raddb/sites-enabled/default
+group post-auth {
++[exec] = noop
+} # group post-auth = noop
Sending Access-Accept of id 114 to 192.168.3.74 port 53233
Finished request 1.
Going to the next request
Waking up in 4.9 seconds.
rad_recv: Accounting-Request packet from host 192.168.3.74 port 53233, id=115, length=263
        User-Name = "spirent0"
        Acct-Status-Type = Start
        Acct-Session-Id = "34"
        Service-Type = Framed-User
        Framed-Protocol = PPP
        ERX-Attr-177 = 0x506f72742053706565643a2031303030303030306b
        Acct-Authentic = RADIUS
        Acct-Delay-Time = 0
        Calling-Station-Id = "MX104-RE0:ps0.1073741837-0/0/0.0:11"
        ERX-Dhcp-Mac-Addr = "0010.9400.0007"
        Event-Timestamp = "Oct 16 2014 11:21:53 UTC"
        Framed-IP-Address = 192.168.0.106
        Framed-IP-Netmask = 255.255.255.0
        ERX-Interface-Desc = "-- (P)seudowire (S)ervice interface"
        NAS-Identifier = "MX104-RE0"
        NAS-Port = 11
        NAS-Port-Id = "ps0.1073741837-0/0/0.0:11"
        NAS-Port-Type = Ethernet
# Executing section preacct from file /usr/local/etc/raddb/sites-enabled/default
+group preacct {
++[preprocess] = ok
[acct_unique] Hashing 'NAS-Port = 11,NAS-Identifier = "MX104-RE0",NAS-IP-Address = 192.168.3.74,Acct-Session-Id = "34",User-Name = "spirent0"'
[acct_unique] Acct-Unique-Session-ID = "e90db3d7c8afcbf4".
++[acct_unique] = ok
[suffix] No '@' in User-Name = "spirent0", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] = noop
++[files] = noop
+} # group preacct = ok
# Executing section accounting from file /usr/local/etc/raddb/sites-enabled/default
+group accounting {
[detail]        expand: %{Packet-Src-IP-Address} -> 192.168.3.74
[detail]        expand: /var/log/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/detail-%Y%m%d -> /var/log/radacct/192.168.3.74/detail-20141016
[detail] /var/log/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/detail-%Y%m%d expands to /var/log/radacct/192.168.3.74/detail-20141016
[detail]        expand: %t -> Thu Oct 16 15:40:50 2014
++[detail] = ok
++[exec] = noop
[attr_filter.accounting_response]       expand: %{User-Name} -> spirent0
attr_filter: Matched entry DEFAULT at line 12
++[attr_filter.accounting_response] = updated
+} # group accounting = updated
Sending Accounting-Response of id 115 to 192.168.3.74 port 53233
Finished request 2.
Cleaning up request 2 ID 115 with timestamp +14
Going to the next request
Waking up in 4.8 seconds.
rad_recv: Accounting-Request packet from host 192.168.3.74 port 53233, id=116, length=263
        User-Name = "spirent1"
        Acct-Status-Type = Start
        Acct-Session-Id = "35"
        Service-Type = Framed-User
        Framed-Protocol = PPP
        ERX-Attr-177 = 0x506f72742053706565643a2031303030303030306b
        Acct-Authentic = RADIUS
        Acct-Delay-Time = 0
        Calling-Station-Id = "MX104-RE0:ps0.1073741837-0/0/0.0:11"
        ERX-Dhcp-Mac-Addr = "0010.9400.0008"
        Event-Timestamp = "Oct 16 2014 11:21:53 UTC"
        Framed-IP-Address = 192.168.0.107
        Framed-IP-Netmask = 255.255.255.0
        ERX-Interface-Desc = "-- (P)seudowire (S)ervice interface"
        NAS-Identifier = "MX104-RE0"
        NAS-Port = 11
        NAS-Port-Id = "ps0.1073741837-0/0/0.0:11"
        NAS-Port-Type = Ethernet
# Executing section preacct from file /usr/local/etc/raddb/sites-enabled/default
+group preacct {
++[preprocess] = ok
[acct_unique] Hashing 'NAS-Port = 11,NAS-Identifier = "MX104-RE0",NAS-IP-Address = 192.168.3.74,Acct-Session-Id = "35",User-Name = "spirent1"'
[acct_unique] Acct-Unique-Session-ID = "f1bb8846a2b77ce9".
++[acct_unique] = ok
[suffix] No '@' in User-Name = "spirent1", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] = noop
++[files] = noop
+} # group preacct = ok
# Executing section accounting from file /usr/local/etc/raddb/sites-enabled/default
+group accounting {
[detail]        expand: %{Packet-Src-IP-Address} -> 192.168.3.74
[detail]        expand: /var/log/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/detail-%Y%m%d -> /var/log/radacct/192.168.3.74/detail-20141016
[detail] /var/log/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/detail-%Y%m%d expands to /var/log/radacct/192.168.3.74/detail-20141016
[detail]        expand: %t -> Thu Oct 16 15:40:50 2014
++[detail] = ok
++[exec] = noop
[attr_filter.accounting_response]       expand: %{User-Name} -> spirent1
attr_filter: Matched entry DEFAULT at line 12
++[attr_filter.accounting_response] = updated
+} # group accounting = updated
Sending Accounting-Response of id 116 to 192.168.3.74 port 53233
Finished request 3.
Cleaning up request 3 ID 116 with timestamp +14
Going to the next request
Waking up in 4.8 seconds.
rad_recv: Accounting-Request packet from host 192.168.3.74 port 53233, id=117, length=401
        User-Name = "spirent0"
        Acct-Status-Type = Interim-Update
        Acct-Session-Id = "34"
        Acct-Input-Octets = 0
        Acct-Output-Octets = 0
        Acct-Session-Time = 1
        Acct-Input-Packets = 0
        Acct-Output-Packets = 0
        Service-Type = Framed-User
        Framed-Protocol = PPP
        ERX-Attr-177 = 0x506f72742053706565643a2031303030303030306b
        Acct-Authentic = RADIUS
        Acct-Delay-Time = 0
        Calling-Station-Id = "MX104-RE0:ps0.1073741837-0/0/0.0:11"
        ERX-Dhcp-Mac-Addr = "0010.9400.0007"
        Event-Timestamp = "Oct 16 2014 11:21:54 UTC"
        Framed-IP-Address = 192.168.0.106
        Framed-IP-Netmask = 255.255.255.0
        ERX-Input-Gigapkts = 0
        Acct-Input-Gigawords = 0
        ERX-Interface-Desc = "-- (P)seudowire (S)ervice interface"
        NAS-Identifier = "MX104-RE0"
        NAS-Port = 11
        NAS-Port-Id = "ps0.1073741837-0/0/0.0:11"
        NAS-Port-Type = Ethernet
        ERX-Output-Gigapkts = 0
        Acct-Output-Gigawords = 0
        ERX-IPv6-Acct-Input-Octets = 0
        ERX-IPv6-Acct-Output-Octets = 0
        ERX-IPv6-Acct-Input-Packets = 0
        ERX-IPv6-Acct-Output-Packets = 0
        ERX-IPv6-Acct-Input-Gigawords = 0
        ERX-IPv6-Acct-Output-Gigawords = 0
# Executing section preacct from file /usr/local/etc/raddb/sites-enabled/default
+group preacct {
++[preprocess] = ok
[acct_unique] Hashing 'NAS-Port = 11,NAS-Identifier = "MX104-RE0",NAS-IP-Address = 192.168.3.74,Acct-Session-Id = "34",User-Name = "spirent0"'
[acct_unique] Acct-Unique-Session-ID = "e90db3d7c8afcbf4".
++[acct_unique] = ok
[suffix] No '@' in User-Name = "spirent0", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] = noop
++[files] = noop
+} # group preacct = ok
# Executing section accounting from file /usr/local/etc/raddb/sites-enabled/default
+group accounting {
[detail]        expand: %{Packet-Src-IP-Address} -> 192.168.3.74
[detail]        expand: /var/log/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/detail-%Y%m%d -> /var/log/radacct/192.168.3.74/detail-20141016
[detail] /var/log/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/detail-%Y%m%d expands to /var/log/radacct/192.168.3.74/detail-20141016
[detail]        expand: %t -> Thu Oct 16 15:40:51 2014
++[detail] = ok
++[exec] = noop
[attr_filter.accounting_response]       expand: %{User-Name} -> spirent0
attr_filter: Matched entry DEFAULT at line 12
++[attr_filter.accounting_response] = updated
+} # group accounting = updated
Sending Accounting-Response of id 117 to 192.168.3.74 port 53233
Finished request 4.
Cleaning up request 4 ID 117 with timestamp +15
Going to the next request
Waking up in 4.2 seconds.
rad_recv: Accounting-Request packet from host 192.168.3.74 port 53233, id=118, length=401
        User-Name = "spirent1"
        Acct-Status-Type = Interim-Update
        Acct-Session-Id = "35"
        Acct-Input-Octets = 0
        Acct-Output-Octets = 0
        Acct-Session-Time = 1
        Acct-Input-Packets = 0
        Acct-Output-Packets = 0
        Service-Type = Framed-User
        Framed-Protocol = PPP
        ERX-Attr-177 = 0x506f72742053706565643a2031303030303030306b
        Acct-Authentic = RADIUS
        Acct-Delay-Time = 0
        Calling-Station-Id = "MX104-RE0:ps0.1073741837-0/0/0.0:11"
        ERX-Dhcp-Mac-Addr = "0010.9400.0008"
        Event-Timestamp = "Oct 16 2014 11:21:54 UTC"
        Framed-IP-Address = 192.168.0.107
        Framed-IP-Netmask = 255.255.255.0
        ERX-Input-Gigapkts = 0
        Acct-Input-Gigawords = 0
        ERX-Interface-Desc = "-- (P)seudowire (S)ervice interface"
        NAS-Identifier = "MX104-RE0"
        NAS-Port = 11
        NAS-Port-Id = "ps0.1073741837-0/0/0.0:11"
        NAS-Port-Type = Ethernet
        ERX-Output-Gigapkts = 0
        Acct-Output-Gigawords = 0
        ERX-IPv6-Acct-Input-Octets = 0
        ERX-IPv6-Acct-Output-Octets = 0
        ERX-IPv6-Acct-Input-Packets = 0
        ERX-IPv6-Acct-Output-Packets = 0
        ERX-IPv6-Acct-Input-Gigawords = 0
        ERX-IPv6-Acct-Output-Gigawords = 0
# Executing section preacct from file /usr/local/etc/raddb/sites-enabled/default
+group preacct {
++[preprocess] = ok
[acct_unique] Hashing 'NAS-Port = 11,NAS-Identifier = "MX104-RE0",NAS-IP-Address = 192.168.3.74,Acct-Session-Id = "35",User-Name = "spirent1"'
[acct_unique] Acct-Unique-Session-ID = "f1bb8846a2b77ce9".
++[acct_unique] = ok
[suffix] No '@' in User-Name = "spirent1", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] = noop
++[files] = noop
+} # group preacct = ok
# Executing section accounting from file /usr/local/etc/raddb/sites-enabled/default
+group accounting {
[detail]        expand: %{Packet-Src-IP-Address} -> 192.168.3.74
[detail]        expand: /var/log/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/detail-%Y%m%d -> /var/log/radacct/192.168.3.74/detail-20141016
[detail] /var/log/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/detail-%Y%m%d expands to /var/log/radacct/192.168.3.74/detail-20141016
[detail]        expand: %t -> Thu Oct 16 15:40:51 2014
++[detail] = ok
++[exec] = noop
[attr_filter.accounting_response]       expand: %{User-Name} -> spirent1
attr_filter: Matched entry DEFAULT at line 12
++[attr_filter.accounting_response] = updated
+} # group accounting = updated
Sending Accounting-Response of id 118 to 192.168.3.74 port 53233
Finished request 5.
Cleaning up request 5 ID 118 with timestamp +15
Going to the next request
Waking up in 4.2 seconds.
Cleaning up request 0 ID 113 with timestamp +14
Cleaning up request 1 ID 114 with timestamp +14
Ready to process requests.


